
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 2 "Execute test 'Roes - Login - Adam'".
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 3 "Comment: ____Go to customer page____"...
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 3 "Comment: ____Go to customer page____".
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:15,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 4 "Click 'RoesNavBarCustomerButton'"...
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 4 "Click 'RoesNavBarCustomerButton'".
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 5 "Comment: ____Make sure you are on the search page____"...
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 5 "Comment: ____Make sure you are on the search page____".
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 6 "Wait for ExistsNot 'LoadSpinner'"...
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 6 "Wait for ExistsNot 'LoadSpinner'".
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 7 "Wait for '500' msec."...
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 7 "Wait for '500' msec.".
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 8 "Verify 'TextContent' 'Contains' 'Customer Search' on 'CustomerSearchH1Tag'"...
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 8 "Verify 'TextContent' 'Contains' 'Customer Search' on 'CustomerSearchH1Tag'".
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 9 "Comment: ____The table should default to 7 rows and 10 columns____"...
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 9 "Comment: ____The table should default to 7 rows and 10 columns____".
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:16,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 10 "Verify table's 'RowsCount' is '10' on 'CustomerSearchTable'"...
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 10 "Verify table's 'RowsCount' is '10' on 'CustomerSearchTable'".
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 11 "Verify table's 'ColumnsCount' is '7' on 'CustomerSearchTable'"...
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 11 "Verify table's 'ColumnsCount' is '7' on 'CustomerSearchTable'".
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 2 "Execute test 'Quick Navigate to Customer Search'".
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 3 "Comment: ____Navigate To shield customer master____"...
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 3 "Comment: ____Navigate To shield customer master____".
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 4 "Execute test 'Navigate to Shield Customer Master'"...
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.InternalExecuteTest() : Executing test: 'Navigate to Shield Customer Master', path: 'Customer Master\Customer Master Reusable Tests\Navigate to Shield Customer Master.tstest.'
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentResult() : VisualDebugger::SetCurrentResult
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 1 "Comment: ____Assuming Already Logged in, Go to shield customer master____"...
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 1 "Comment: ____Assuming Already Logged in, Go to shield customer master____".
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 2 "Execute test 'Customer Search - Shield ViewEdit Button'"...
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.InternalExecuteTest() : Executing test: 'Customer Search - Shield ViewEdit Button', path: 'Customer Search\Customer Search Reusable Tests\Customer Search - Shield ViewEdit Button.tstest.'
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentResult() : VisualDebugger::SetCurrentResult
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 1 "Comment: ____Assuming already logged in, filter for shield____"...
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 1 "Comment: ____Assuming already logged in, filter for shield____".
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:17,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 2 "Enter text '141014' in 'CustomerNumberFilterInput'"...
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 2 "Enter text '141014' in 'CustomerNumberFilterInput'".
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 3 "Wait for '500' msec."...
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 3 "Wait for '500' msec.".
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 4 "IF (Verify Exists 'CustomerSearchNoResults')"...
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 4 "IF (Verify Exists 'CustomerSearchNoResults')".
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 1 "Comment: ____Shield is active, so carry on____"...
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 1 "Comment: ____Shield is active, so carry on____".
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 2 "Verify 'TextContent' 'Contains' '141014' on '1stTableCellCustomerSearch'"...
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 2 "Verify 'TextContent' 'Contains' '141014' on '1stTableCellCustomerSearch'".
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 5 "Click '1stViewEditButton'"...
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 5 "Click '1stViewEditButton'".
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:19,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 6 "Wait for 'TextContent' 'Contains' 'SHIELD Test Customer' on 'SHIELDTestDiv'"...
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 6 "Wait for 'TextContent' 'Contains' 'SHIELD Test Customer' on 'SHIELDTestDiv'".
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 7 "Wait for ExistsNot 'LoadSpinner'"...
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 7 "Wait for ExistsNot 'LoadSpinner'".
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 2 "Execute test 'Customer Search - Shield ViewEdit Button'".
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 4 "Execute test 'Navigate to Shield Customer Master'".
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 5 "Comment: ____Go to files tab____"...
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 5 "Comment: ____Go to files tab____".
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 6 "Click 'CustomerMasterFilesTabLink'"...
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 6 "Click 'CustomerMasterFilesTabLink'".
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 7 "Wait for Exists 'CustomerFilesTree'"...
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 7 "Wait for Exists 'CustomerFilesTree'".
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 8 "Comment: ____Get to the "can you see me" txt file and download it____"...
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 8 "Comment: ____Get to the "can you see me" txt file and download it____".
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:22,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 9 "Click 'CustomerFilesShieldTestFolderSpan'"...
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 9 "Click 'CustomerFilesShieldTestFolderSpan'".
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 10 "Wait for Exists 'CustomerfilesShieldInnerTestFolderSpan'"...
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 10 "Wait for Exists 'CustomerfilesShieldInnerTestFolderSpan'".
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 11 "Click 'CustomerfilesShieldInnerTestFolderSpan'"...
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 11 "Click 'CustomerfilesShieldInnerTestFolderSpan'".
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:23,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 12 "Wait for Exists 'CustomerfilesShieldTestTextFile'"...
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 12 "Wait for Exists 'CustomerfilesShieldTestTextFile'".
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 13 "Click 'CustomerfilesShieldTestTextFile'"...
[06/07 08:35:24,IEXPLORE.EXE(4332:1),Framework] InternetExplorerActions.BeginAsyncInjection() : Spawned Internet Explorer injection thread (HWND=1901654, AssemblyAndClass="C:\Windows\Microsoft.Net\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\v4.0_2019.1.408.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint", PipeName="Pipe.ArtOfTest.WebAii.BrowserProvisioner_-656714760", ProcessId="8532").
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 13 "Click 'CustomerfilesShieldTestTextFile'".
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 14 "Handle 'Logon' dialog."...
[06/07 08:35:24,ArtOfTest.Runner.exe(8296:4),DialogPlayback] BaseDialog.WaitUntilAnyHandled() : Beginning 5000 msec wait for any dialog from the set to be handled {LogonDialog(UserName=ajacobs,Password=*******,Dismiss=OK)}.
[06/07 08:35:24,IEXPLORE.EXE(4332:6)] First trace message from pool thread "Internet Explorer injection thread" (managed ID = 6, native ID = 6036).
[06/07 08:35:24,IEXPLORE.EXE(4332:6),Error] ProcessExtensions.GetEntryModulePath() : EXCEPTION! (see below)
     Outer Exception Type: Telerik.TestingFramework.Interop.Win32.Win32Exception
     Message: ERROR_GEN_FAILURE (31) : A device attached to the system is not functioning
     HRESULT: 0x80004005 (Official ID (if app.) = E_FAIL, Error Bit = FAILED, Facility = FACILITY_NULL, Code = 16389)
     Call Stack:
          at Telerik.TestingFramework.Interop.Win32.KERNEL32.QueryFullProcessImageName(HANDLE hProcess, QueryFullProcessImageNameFlags dwFlags, Int32 iTryBufferLength)
          at ArtOfTest.Common.Extensions.ProcessExtensions.GetEntryModulePath(Process process)

[06/07 08:35:24,IEXPLORE.EXE(4332:6),Framework] Connector.Start() : Process launched (ID=2544, Path="", Arguments=""C:\Program Files (x86)\Progress\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 3081304").
[06/07 08:35:24,IEXPLORE.EXE(4332:6),Error] ProcessExtensions.GetEntryModulePath() : EXCEPTION! (see below)
     Outer Exception Type: Telerik.TestingFramework.Interop.Win32.Win32Exception
     Message: ERROR_GEN_FAILURE (31) : A device attached to the system is not functioning
     HRESULT: 0x80004005 (Official ID (if app.) = E_FAIL, Error Bit = FAILED, Facility = FACILITY_NULL, Code = 16389)
     Call Stack:
          at Telerik.TestingFramework.Interop.Win32.KERNEL32.QueryFullProcessImageName(HANDLE hProcess, QueryFullProcessImageNameFlags dwFlags, Int32 iTryBufferLength)
          at ArtOfTest.Common.Extensions.ProcessExtensions.GetEntryModulePath(Process process)

[06/07 08:35:24,IEXPLORE.EXE(4332:6),Framework] Connector.Start() : Process exited (ID=2544, ExitCode=0, Path="", Arguments=""C:\Program Files (x86)\Progress\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 3081304").
[06/07 08:35:24,IEXPLORE.EXE(4332:6),Framework] Connector.InjectCode() : ------- Function Start -------
[06/07 08:35:24,IEXPLORE.EXE(4332:6),Framework] Connector.InjectCode() : Connection string: C:\Windows\Microsoft.Net\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\v4.0_2019.1.408.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?8532
[06/07 08:35:24,IEXPLORE.EXE(4332:6),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 3081304 on another thread...
[06/07 08:35:24,IEXPLORE.EXE(4332:8)] First trace message from pool thread "WaitAsync polling wait worker" (managed ID = 8, native ID = 2252).
[06/07 08:35:24,IEXPLORE.EXE(4332:8),Framework] <>c__DisplayClass26_3.<WaitForDocument>b__1() : Attempting to get document from window handle
[06/07 08:35:25,IEXPLORE.EXE(4332:6),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[06/07 08:35:25,IEXPLORE.EXE(4332:6),Framework] Connector.InjectCode() : Sending WM_COPYDATA to HWND 3081304 (lpData = "C:\Windows\Microsoft.Net\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\v4.0_2019.1.408.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?8532")...
[06/07 08:35:25,IEXPLORE.EXE(8472:1)] First trace message from process 8472: "C:\Program Files (x86)\Internet Explorer\IEXPLORE.EXE" SCODEF:3184 CREDAT:82957 /prefetch:2
[06/07 08:35:25,IEXPLORE.EXE(8472:1)] First trace message from background unnamed thread (managed ID = 1, native ID = 5660).
[06/07 08:35:25,IEXPLORE.EXE(8472:1),Framework] ArtOfTestPluginEntryPoint.Connect() : The .NET Framework is now active inside the hooked process (HWND = 3081304, PipeName = "Pipe.ArtOfTest.WebAii.BrowserProvisioner_-656714760", PID = 8532).
[06/07 08:35:25,IEXPLORE.EXE(8472:1),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 3081304 on same thread...
[06/07 08:35:25,IEXPLORE.EXE(8472:1),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[06/07 08:35:25,IEXPLORE.EXE(8472:1),Framework] BrowserRemoteClient constructor : The client ID for this hooked process will be "Client_75ce53a7-c52f-4926-aeb1-112e120bc0bf".
[06/07 08:35:25,ArtOfTest.Runner.exe(8296:6),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe.
[06/07 08:35:25,ArtOfTest.Runner.exe(8296:7)] First trace message from background thread "Remoted async command listener" (managed ID = 7, native ID = 8356).
[06/07 08:35:25,ArtOfTest.Runner.exe(8296:7),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Not connected; this will now wait indefinitely for a pipe client connection...
[06/07 08:35:25,IEXPLORE.EXE(8472:1),Framework] BrowserRemoteClient.CreateNamedPipes() : Named pipes created for communication with the server: {Command = "e9b29a1d-c585-479f-990b-80280d55388d.CommandPipe", Async = "e9b29a1d-c585-479f-990b-80280d55388d.AsyncPipe"}
[06/07 08:35:25,ArtOfTest.Runner.exe(8296:7),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A new client has connected to the pipe.
[06/07 08:35:25,ArtOfTest.Runner.exe(8296:7),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Now waiting indefinitely for a command from the pipe client...
[06/07 08:35:25,ArtOfTest.Runner.exe(8296:6),Framework] Manager.AddNewBrowser() : Added client ID "Client_75ce53a7-c52f-4926-aeb1-112e120bc0bf" (now there is/are 2 total).
[06/07 08:35:25,IEXPLORE.EXE(4332:6),Framework] Connector.InjectCode() : Returned from sending WM_COPYDATA (LRESULT=0, GetLastError()=DS_S_SUCCESS).
[06/07 08:35:25,IEXPLORE.EXE(4332:6),Framework] Connector.InjectCode() : ------- Function End -------
[06/07 08:35:26,ArtOfTest.Runner.exe(8296:8)] First trace message from background thread "UAI Dispatcher Thread" (managed ID = 8, native ID = 2096).
[06/07 08:35:26,ArtOfTest.Runner.exe(8296:8),Framework] MUI.GetString() : EXCEPTION! (see below)
     Situation: Unable to localize string #2030 in module C:\Windows\system32\en-US\wininet.dll.mui
     Outer Exception Type: System.ArgumentOutOfRangeException
     Message: Length cannot be less than zero.
          Parameter name: length
     HRESULT: 0x80131502 (Official ID (if app.) = COR_E_ARGUMENTOUTOFRANGE, Error Bit = FAILED, Facility = FACILITY_URT, Code = 5378)
     Call Stack:
          at System.String.Substring(Int32 startIndex, Int32 length)
          at ArtOfTest.WebAii.Win32.Dialogs.LogonDialog.<>c.<.cctor>b__29_0(String s)
          at ArtOfTest.Common.MUI.GetString(String module, Int32 Id, String defaultValue, Func`2 func)

[06/07 08:35:26,ArtOfTest.Runner.exe(8296:8),DialogPlayback] DialogMonitor.HandleDialogWindow() : LogonDialog(UserName=ajacobs,Password=*******,Dismiss=OK) detected, now attempting to handle it.
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:8),DialogPlayback] DialogMonitor.HandleDialogWindow() : LogonDialog(UserName=ajacobs,Password=*******,Dismiss=OK) handled.
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),DialogPlayback] BaseDialog.WaitUntilAnyHandled() : LogonDialog(UserName=ajacobs,Password=*******,Dismiss=OK) handling was detected after 4944 msec.
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 14 "Handle 'Logon' dialog.".
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 16 "Comment: ____Currently Bugged - Apparently it was the popup window____"...
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 16 "Comment: ____Currently Bugged - Apparently it was the popup window____".
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:4),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 17 "Handle 'Download' dialog."...
[06/07 08:35:29,IEXPLORE.EXE(8472:1),Framework] BrowserRemoteClient.Disconnect() : Sending ClientDisconnectRequest(ClientId="Client_75ce53a7-c52f-4926-aeb1-112e120bc0bf") to pipe server...
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:7),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A ClientDisconnectRequest(ClientId="Client_75ce53a7-c52f-4926-aeb1-112e120bc0bf") has been received from the pipe client.
[06/07 08:35:29,IEXPLORE.EXE(8472:1),Framework] BrowserRemoteClient.Disconnect() : Command pipe is already disconnected.
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:7),Framework] Manager.RemoveBrowser() : Removed client ID "Client_75ce53a7-c52f-4926-aeb1-112e120bc0bf" (1 remaining).
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:7),Framework] Manager.SetActiveBrowser() : Active browser is now "Client_24c866be-9831-4533-b7da-510c464abce3".
[06/07 08:35:29,ArtOfTest.Runner.exe(8296:7),Framework] BrowserRemoted.End() : Now aborting the listener thread (TID = 7).
[06/07 08:35:32,ArtOfTest.Runner.exe(8296:8),DialogPlayback] DialogMonitor.OnWindowCreated() : New dialog detected (ClassName = "#32770", Handle = "17498866").
[06/07 08:35:34,ArtOfTest.Runner.exe(8296:8),DialogPlayback] DialogMonitor.OnWindowCreated() : New dialog detected (ClassName = "Frame Notification Bar", Handle = "1967190").
[06/07 08:35:35,ArtOfTest.Runner.exe(8296:8),DialogPlayback] DialogMonitor.HandleDialogWindow() : IE9DownloadNotificationBar(Dismiss=SAVE) detected, now attempting to handle it.
[06/07 08:35:36,ArtOfTest.Runner.exe(8296:8),DialogPlayback] DialogMonitor.HandleDialogWindow() : IE9DownloadNotificationBar(Dismiss=SAVE) handled.
[06/07 08:35:37,ArtOfTest.Runner.exe(8296:8),DialogPlayback] DialogMonitor.OnWindowCreated() : New dialog detected (ClassName = "#32770", Handle = "19727108").
[06/07 08:35:38,ArtOfTest.Runner.exe(8296:8),DialogPlayback] DialogMonitor.HandleDialogWindow() : SaveAsDialog(Dismiss=SAVE) detected, now attempting to handle it.
[06/07 08:35:38,ArtOfTest.Runner.exe(8296:8),DialogPlayback] SaveAsDialog.Handle() : Handle save dialog
[06/07 08:35:42,ArtOfTest.Runner.exe(8296:8),DialogPlayback] DialogMonitor.HandleDialogWindow() : SaveAsDialog(Dismiss=SAVE) handled.
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),DialogPlayback] DownloadDialogHandlerDescriptor.Execute() : Timed out waiting '30000' msec. for download dialog to be handled.
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Error] ExecutionEngine.CatchExecuteStepException() : EXCEPTION! (see below)
     Outer Exception Type: System.TimeoutException
     Message: Timed out waiting '30000' msec. for download dialog to be handled.
     HRESULT: 0x80131505 (Official ID (if app.) = COR_E_TIMEOUT, Error Bit = FAILED, Facility = FACILITY_URT, Code = 5381)
     Call Stack:
          at ArtOfTest.WebAii.Design.IntrinsicTranslators.Descriptors.DownloadDialogHandlerDescriptor.Execute(Browser browser)
          at ArtOfTest.WebAii.Design.IntrinsicTranslators.Descriptors.DialogHandlerDescriptor.Execute(IAutomationHost browser)
          at ArtOfTest.WebAii.Design.Execution.ExecutionEngine.ExecuteStep(Int32 order)

[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::BreakOnFail
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::Start
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::ShutDown::Start
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DetachWrappedWindow::Start
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DetachWrappedWindow::End
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DispatcherBeginInvokeShutdown::Start
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::Close::Start
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::End
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Framework] BrowserProvisioner.EndService() : Connecting to the provisioning pipe "Pipe.ArtOfTest.WebAii.BrowserProvisioner_-656714760" in order to unblock and eventually terminate it...
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Framework] BrowserProvisioner.EndService() : Provisioning pipe connected.
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:6),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe but this will be treated as a termination cue.
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Framework] BrowserProvisioner.EndService() : Provisioning thread terminated.
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),DialogPlayback] DialogMonitor.AddDialog() : Added {OnBeforeUnloadDialog(Dismiss=OK)} for monitoring.
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Framework] Manager.RemoveBrowser() : Removed client ID "Client_24c866be-9831-4533-b7da-510c464abce3" (0 remaining).
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Framework] Manager.SetActiveBrowser() : Active browser is now null.
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:4),Framework] BrowserRemoted.End() : Now aborting the listener thread (TID = 13).
[06/07 08:36:00,IEXPLORE.EXE(4332:1),Framework] BrowserRemoteClient.Disconnect() : Sending ClientDisconnectRequest(ClientId="Client_24c866be-9831-4533-b7da-510c464abce3") to pipe server...
[06/07 08:36:00,IEXPLORE.EXE(4332:1),Framework] BrowserRemoteClient.Disconnect() : Command pipe is already disconnected.
[06/07 08:36:00,ArtOfTest.Runner.exe(8296:13),Warning] PipeCommunication.SyncPipeRead() : Pipe read broken by thread-abort.
[06/07 08:36:03,ArtOfTest.Runner.exe(8296:4),DialogPlayback] DialogMonitor.Stop() : Dialog monitoring is being halted.
[06/07 08:36:03,ArtOfTest.Runner.exe(8296:4),UIAutomation] AutomationExtensions.AddAutomationEventHandler() : Added a(n) WindowPatternIdentifiers.WindowOpenedProperty handler on element System.Windows.Automation.AutomationElement scope Descendants.
[06/07 08:36:04,Telerik.TestStudio.Desktop.exe(8532:7)] First trace message from background thread "Callback Listener Thread" (managed ID = 7, native ID = 2652).
[06/07 08:36:04,Telerik.TestStudio.Desktop.exe(8532:7),Warning] PipeCommunication.SyncPipeRead() : Pipe was already disposed at the moment of the read attempt.
